bng-test/usr/local/etc/raddb# cat users
000c.29eb.eb96          Cleartext-Password := "123"

000c.297c.ea3f          Cleartext-Password := "123"

spirent0                Cleartext-Password := "spirent0"
                        ERX-Service-Activate:1 += "RATE-LIMIT(1000000)"

spirent1                Cleartext-Password := "spirent1"
                        ERX-Service-Activate:1 += "RATE-LIMIT(1000000)"

===

rad_recv: Access-Request packet from host 192.168.3.74 port 53233, id=149, length=274
        User-Name = "spirent0"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        CHAP-Password = 0x191bec2c5b08e7e1ecc0f4ee7ef7b19ff6
        CHAP-Challenge = 0x08523247b57a0669bd73f7434d3e2f75f71ce40e170a78d18ed7c797
        Chargeable-User-Identity = ""
        Acct-Session-Id = "182"
        Calling-Station-Id = "MX104-RE0:xe-0/0/0.1073741929:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0013"
        ERX-Interface-Desc = "-- L2 access network"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "xe-0/0/0.1073741929:11"
        NAS-Port-Type = Ethernet
        ADSL-Agent-Circuit-Id = "circuit Port //4/7-1"
        ADSL-Agent-Remote-Id = "remote 1.2.3.4"
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/default
+group authorize {
++[preprocess] = ok
[chap] Setting 'Auth-Type := CHAP'
++[chap] = ok
++[mschap] = noop
++[digest] = noop
[suffix] No '@' in User-Name = "spirent0", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
[eap] No EAP-Message, not doing EAP
++[eap] = noop
[files] users: Matched entry spirent0 at line 5
++[files] = ok
++[expiration] = noop
++[logintime] = noop
[pap] WARNING: Auth-Type already set.  Not setting to PAP
++[pap] = noop
+} # group authorize = ok
Found Auth-Type = CHAP
# Executing group from file /usr/local/etc/raddb/sites-enabled/default
+group CHAP {
[chap] login attempt by "spirent0" with CHAP password
[chap] Using clear text password "spirent0" for user spirent0 authentication.
[chap] chap user spirent0 authenticated succesfully
++[chap] = ok
+} # group CHAP = ok
Login OK: [spirent0/<CHAP-Password>] (from client mx104-RE0 port 11 cli MX104-RE0:xe-0/0/0.1073741929:11)
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/default
+group post-auth {
++[exec] = noop
+} # group post-auth = noop
Sending Access-Accept of id 149 to 192.168.3.74 port 53233
        ERX-Service-Activate:1 += "RATE-LIMIT(1000000)"
Finished request 0.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Access-Request packet from host 192.168.3.74 port 53233, id=150, length=269
        User-Name = "spirent1"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        CHAP-Password = 0x0a8dee752eba80988c5f225835d63fb65e
        CHAP-Challenge = 0x354127537e3766011fafcd71be3812326af5666a7798c6
        Chargeable-User-Identity = ""
        Acct-Session-Id = "183"
        Calling-Station-Id = "MX104-RE0:xe-0/0/0.1073741929:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0014"
        ERX-Interface-Desc = "-- L2 access network"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "xe-0/0/0.1073741929:11"
        NAS-Port-Type = Ethernet
        ADSL-Agent-Circuit-Id = "circuit Port //4/7-1"
        ADSL-Agent-Remote-Id = "remote 1.2.3.4"
# Executing section authorize from file /usr/local/etc/raddb/sites-enabled/default
+group authorize {
++[preprocess] = ok
[chap] Setting 'Auth-Type := CHAP'
++[chap] = ok
++[mschap] = noop
++[digest] = noop
[suffix] No '@' in User-Name = "spirent1", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
[eap] No EAP-Message, not doing EAP
++[eap] = noop
[files] users: Matched entry spirent1 at line 8
++[files] = ok
++[expiration] = noop
++[logintime] = noop
[pap] WARNING: Auth-Type already set.  Not setting to PAP
++[pap] = noop
+} # group authorize = ok
Found Auth-Type = CHAP
# Executing group from file /usr/local/etc/raddb/sites-enabled/default
+group CHAP {
[chap] login attempt by "spirent1" with CHAP password
[chap] Using clear text password "spirent1" for user spirent1 authentication.
[chap] chap user spirent1 authenticated succesfully
++[chap] = ok
+} # group CHAP = ok
Login OK: [spirent1/<CHAP-Password>] (from client mx104-RE0 port 11 cli MX104-RE0:xe-0/0/0.1073741929:11)
# Executing section post-auth from file /usr/local/etc/raddb/sites-enabled/default
+group post-auth {
++[exec] = noop
+} # group post-auth = noop
Sending Access-Accept of id 150 to 192.168.3.74 port 53233
        ERX-Service-Activate:1 += "RATE-LIMIT(1000000)"
Finished request 1.
Going to the next request
Waking up in 4.9 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=151, length=287
        User-Name = "spirent0"
        Acct-Status-Type = Start
        Acct-Session-Id = "182"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:xe-0/0/0.1073741929:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0013"
        Event-Timestamp = "Oct 20 2014 08:54:23 UTC"
        Framed-IP-Address = 192.168.0.128
        Framed-IP-Netmask = 255.255.255.0
        ERX-Interface-Desc = "-- L2 access network"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "xe-0/0/0.1073741929:11"
        NAS-Port-Type = Ethernet
        ADSL-Agent-Circuit-Id = "circuit Port //4/7-1"
        ADSL-Agent-Remote-Id = "remote 1.2.3.4"
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "182",User-Name = "spirent0"'
[acct_unique] Acct-Unique-Session-ID = "c6b61ea124a2d2b9".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent0", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141020
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141020
[detail]        expand: %t -> Mon Oct 20 13:13:37 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent0
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 151 to 192.168.3.74 port 53233
Finished request 2.
Cleaning up request 2 ID 151 with timestamp +207
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=152, length=287
        User-Name = "spirent1"
        Acct-Status-Type = Start
        Acct-Session-Id = "183"
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:xe-0/0/0.1073741929:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0014"
        Event-Timestamp = "Oct 20 2014 08:54:23 UTC"
        Framed-IP-Address = 192.168.0.129
        Framed-IP-Netmask = 255.255.255.0
        ERX-Interface-Desc = "-- L2 access network"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "xe-0/0/0.1073741929:11"
        NAS-Port-Type = Ethernet
        ADSL-Agent-Circuit-Id = "circuit Port //4/7-1"
        ADSL-Agent-Remote-Id = "remote 1.2.3.4"
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "183",User-Name = "spirent1"'
[acct_unique] Acct-Unique-Session-ID = "99755bface1c0673".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent1", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141020
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141020
[detail]        expand: %t -> Mon Oct 20 13:13:37 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent1
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 152 to 192.168.3.74 port 53233
Finished request 3.
Cleaning up request 3 ID 152 with timestamp +207
Going to the next request
Waking up in 4.7 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=153, length=425
        User-Name = "spirent0"
        Acct-Status-Type = Interim-Update
        Acct-Session-Id = "182"
        Acct-Input-Octets = 0
        Acct-Output-Octets = 0
        Acct-Session-Time = 1
        Acct-Input-Packets = 0
        Acct-Output-Packets = 0
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:xe-0/0/0.1073741929:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0013"
        Event-Timestamp = "Oct 20 2014 08:54:24 UTC"
        Framed-IP-Address = 192.168.0.128
        Framed-IP-Netmask = 255.255.255.0
        ERX-Input-Gigapkts = 0
        Acct-Input-Gigawords = 0
        ERX-Interface-Desc = "-- L2 access network"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "xe-0/0/0.1073741929:11"
        NAS-Port-Type = Ethernet
        ERX-Output-Gigapkts = 0
        Acct-Output-Gigawords = 0
        ERX-IPv6-Acct-Input-Octets = 0
        ERX-IPv6-Acct-Output-Octets = 0
        ERX-IPv6-Acct-Input-Packets = 0
        ERX-IPv6-Acct-Output-Packets = 0
        ERX-IPv6-Acct-Input-Gigawords = 0
        ERX-IPv6-Acct-Output-Gigawords = 0
        ADSL-Agent-Circuit-Id = "circuit Port //4/7-1"
        ADSL-Agent-Remote-Id = "remote 1.2.3.4"
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "182",User-Name = "spirent0"'
[acct_unique] Acct-Unique-Session-ID = "c6b61ea124a2d2b9".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent0", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141020
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141020
[detail]        expand: %t -> Mon Oct 20 13:13:37 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent0
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 153 to 192.168.3.74 port 53233
Finished request 4.
Cleaning up request 4 ID 153 with timestamp +207
Going to the next request
Waking up in 4.2 seconds.
rad_recv: Accounting-Request packet from host 192.168.3.74 port 53233, id=154, length=425
        User-Name = "spirent1"
        Acct-Status-Type = Interim-Update
        Acct-Session-Id = "183"
        Acct-Input-Octets = 0
        Acct-Output-Octets = 0
        Acct-Session-Time = 1
        Acct-Input-Packets = 0
        Acct-Output-Packets = 0
        Service-Type = Framed-User
        Framed-Protocol = PPP
        ERX-Attr-177 = 0x506f72742053706565643a2031303030303030306b
        Acct-Authentic = RADIUS
        Acct-Delay-Time = 0
        Calling-Station-Id = "MX104-RE0:xe-0/0/0.1073741929:11"
        ERX-Dhcp-Mac-Addr = "0010.9400.0014"
        Event-Timestamp = "Oct 20 2014 08:54:24 UTC"
        Framed-IP-Address = 192.168.0.129
        Framed-IP-Netmask = 255.255.255.0
        ERX-Input-Gigapkts = 0
        Acct-Input-Gigawords = 0
        ERX-Interface-Desc = "-- L2 access network"
        NAS-Identifier = "MX104-RE0"
        NAS-Port = 11
        NAS-Port-Id = "xe-0/0/0.1073741929:11"
        NAS-Port-Type = Ethernet
        ERX-Output-Gigapkts = 0
        Acct-Output-Gigawords = 0
        ERX-IPv6-Acct-Input-Octets = 0
        ERX-IPv6-Acct-Output-Octets = 0
        ERX-IPv6-Acct-Input-Packets = 0
        ERX-IPv6-Acct-Output-Packets = 0
        ERX-IPv6-Acct-Input-Gigawords = 0
        ERX-IPv6-Acct-Output-Gigawords = 0
        ADSL-Agent-Circuit-Id = "circuit Port //4/7-1"
        ADSL-Agent-Remote-Id = "remote 1.2.3.4"
# Executing section preacct from file /usr/local/etc/raddb/sites-enabled/default
+group preacct {
++[preprocess] = ok
[acct_unique] Hashing 'NAS-Port = 11,NAS-Identifier = "MX104-RE0",NAS-IP-Address = 192.168.3.74,Acct-Session-Id = "183",User-Name = "spirent1"'
[acct_unique] Acct-Unique-Session-ID = "99755bface1c0673".
++[acct_unique] = ok
[suffix] No '@' in User-Name = "spirent1", looking up realm NULL
[suffix] No such realm "NULL"
++[suffix] = noop
++[files] = noop
+} # group preacct = ok
# Executing section accounting from file /usr/local/etc/raddb/sites-enabled/default
+group accounting {
[detail]        expand: %{Packet-Src-IP-Address} -> 192.168.3.74
[detail]        expand: /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d -> /var/log/radacct/192.168.3.74/detail-20141020
[detail] /var/log/radacct/%{%{Packet-Src-IP-Address}:-%{Packet-Src-IPv6-Address}}/detail-%Y%m%d expands to /var/log/radacct/192.168.3.74/detail-20141020
[detail]        expand: %t -> Mon Oct 20 13:13:37 2014
++[detail] = ok
++[exec] = noop
[attr_filter.accounting_response]       expand: %{User-Name} -> spirent1
attr_filter: Matched entry DEFAULT at line 12
++[attr_filter.accounting_response] = updated
+} # group accounting = updated
Sending Accounting-Response of id 154 to 192.168.3.74 port 53233
Finished request 5.
Cleaning up request 5 ID 154 with timestamp +207
Going to the next request
Waking up in 4.2 seconds.
Cleaning up request 0 ID 149 with timestamp +206
Cleaning up request 1 ID 150 with timestamp +206
Ready to process requests.
